Profile of (eval 1141)[CGI.pm:932]

Filename	(eval 1141)[/usr/share/perl5/CGI.pm:932]
Statements	Executed 4 statements in 10µs
Eval Invoked At	/usr/share/perl5/CGI.pm line 932
Sibling evals	1, 2, 3, 4, 5, 6

Subroutines
Calls	P	F	Exclusive Time	Inclusive Time	Subroutine
4	1	1	508µs	562µs	CGI::::cacheCGI::cache
71	4	2	104µs	104µs	CGI::::CORE:matchCGI::CORE:match (opcode)
68	2	1	67µs	67µs	CGI::::CORE:regcompCGI::CORE:regcomp (opcode)
66	3	2	38µs	38µs	CGI::::CORE:substCGI::CORE:subst (opcode)
32	1	1	20µs	20µs	CGI::::CORE:substcontCGI::CORE:substcont (opcode)

Call graph for these subroutines as a Graphviz dot language file.

Line	State ments	Time on line	Calls	Time in subs	Code
1					# spent 562µs (508+54) within CGI::cache which was called 4 times, avg 141µs/call: # 4 times (508µs+54µs) by CGI::header at line 76 of (eval 1139)[CGI.pm:932], avg 141µs/call package CGI; sub cache {
2	1	4µs	5	56µs	my($self,$new_value) = self_or_default(@_); # spent 56µs making 5 calls to CGI::self_or_default, avg 11µs/call
3	1	2µs			$new_value = '' unless $new_value;
4	1	500ns			if ($new_value ne '') {
5					$self->{'cache'} = $new_value;
6					}
7	1	3µs			return $self->{'cache'};
8					}
9
10					;

					# spent 104µs within CGI::CORE:match which was called 71 times, avg 1µs/call: # 34 times (27µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 31 of (eval 1139)[CGI.pm:932], avg 794ns/call # 16 times (64µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 50 of (eval 1139)[CGI.pm:932], avg 4µs/call # 16 times (3µs+0s) by C4::Output::output_with_http_headers or CGI::unescapeHTML at line 6 of (eval 1140)[CGI.pm:932], avg 188ns/call # 5 times (10µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 54 of (eval 1139)[CGI.pm:932], avg 2µs/call sub CGI::CORE:match; # opcode
					# spent 67µs within CGI::CORE:regcomp which was called 68 times, avg 988ns/call: # 34 times (35µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 28 of (eval 1139)[CGI.pm:932], avg 1µs/call # 34 times (32µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 31 of (eval 1139)[CGI.pm:932], avg 938ns/call sub CGI::CORE:regcomp; # opcode
					# spent 38µs within CGI::CORE:subst which was called 66 times, avg 570ns/call: # 34 times (11µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 28 of (eval 1139)[CGI.pm:932], avg 321ns/call # 16 times (21µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 51 of (eval 1139)[CGI.pm:932], avg 1µs/call # 16 times (6µs+0s) by C4::Output::output_with_http_headers or CGI::unescapeHTML at line 9 of (eval 1140)[CGI.pm:932], avg 350ns/call sub CGI::CORE:subst; # opcode
					# spent 20µs within CGI::CORE:substcont which was called 32 times, avg 625ns/call: # 32 times (20µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 51 of (eval 1139)[CGI.pm:932], avg 625ns/call sub CGI::CORE:substcont; # opcode